[INFO] fetching crate ros2args 0.5.4...
[INFO] testing ros2args-0.5.4 against try#0abe69e6c16114311cc2700e972492e64d69c28f for pr-154065-1
[INFO] extracting crate ros2args 0.5.4 into /workspace/builds/worker-4-tc2/source
[INFO] started tweaking crates.io crate ros2args 0.5.4
[INFO] removed 0 missing examples
[INFO] removed 0 missing tests
[INFO] finished tweaking crates.io crate ros2args 0.5.4
[INFO] tweaked toml for crates.io crate ros2args 0.5.4 written to /workspace/builds/worker-4-tc2/source/Cargo.toml
[INFO] validating manifest of crates.io crate ros2args 0.5.4 on toolchain 0abe69e6c16114311cc2700e972492e64d69c28f
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate crates.io crate ros2args 0.5.4 already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] a3f59638c1522df98ff980ce1a56b5881f7769df4461ac1e39e211f4d7b8b5e9
[INFO] running `Command { std: "docker" "start" "-a" "a3f59638c1522df98ff980ce1a56b5881f7769df4461ac1e39e211f4d7b8b5e9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "a3f59638c1522df98ff980ce1a56b5881f7769df4461ac1e39e211f4d7b8b5e9", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "a3f59638c1522df98ff980ce1a56b5881f7769df4461ac1e39e211f4d7b8b5e9", kill_on_drop: false }`
[INFO] [stdout] a3f59638c1522df98ff980ce1a56b5881f7769df4461ac1e39e211f4d7b8b5e9
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 2d7786625071ec6f8e014ecc7917e1b3f70d5e2b62b036506cb5cbcdf7e9ab0c
[INFO] running `Command { std: "docker" "start" "-a" "2d7786625071ec6f8e014ecc7917e1b3f70d5e2b62b036506cb5cbcdf7e9ab0c", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling foldhash v0.2.0
[INFO] [stderr]    Compiling regex-syntax v0.8.8
[INFO] [stderr]    Compiling thiserror v2.0.17
[INFO] [stderr]    Compiling arraydeque v0.5.1
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling aho-corasick v1.1.4
[INFO] [stderr]    Compiling hashlink v0.11.0
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling yaml-rust2 v0.11.0
[INFO] [stderr]    Compiling regex-automata v0.4.13
[INFO] [stderr]    Compiling thiserror-impl v2.0.17
[INFO] [stderr]    Compiling regex v1.12.2
[INFO] [stderr]    Compiling ros2args v0.5.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 10.45s
[INFO] running `Command { std: "docker" "inspect" "2d7786625071ec6f8e014ecc7917e1b3f70d5e2b62b036506cb5cbcdf7e9ab0c", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "2d7786625071ec6f8e014ecc7917e1b3f70d5e2b62b036506cb5cbcdf7e9ab0c", kill_on_drop: false }`
[INFO] [stdout] 2d7786625071ec6f8e014ecc7917e1b3f70d5e2b62b036506cb5cbcdf7e9ab0c
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 8cb820ac4089c8cb2eccbe790792194c1a68467b7fd2b5031726082a96ddbf9e
[INFO] running `Command { std: "docker" "start" "-a" "8cb820ac4089c8cb2eccbe790792194c1a68467b7fd2b5031726082a96ddbf9e", kill_on_drop: false }`
[INFO] [stderr]    Compiling libc v0.2.178
[INFO] [stderr]    Compiling once_cell v1.21.3
[INFO] [stderr]    Compiling getrandom v0.3.4
[INFO] [stderr]    Compiling tempfile v3.24.0
[INFO] [stderr]    Compiling ros2args v0.5.4 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 3.45s
[INFO] running `Command { std: "docker" "inspect" "8cb820ac4089c8cb2eccbe790792194c1a68467b7fd2b5031726082a96ddbf9e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "8cb820ac4089c8cb2eccbe790792194c1a68467b7fd2b5031726082a96ddbf9e", kill_on_drop: false }`
[INFO] [stdout] 8cb820ac4089c8cb2eccbe790792194c1a68467b7fd2b5031726082a96ddbf9e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-4-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+0abe69e6c16114311cc2700e972492e64d69c28f" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 02ad1eb0aeb153e44d2541942072d0c4c8d7bf5aeb898b94483780d726deb7cb
[INFO] running `Command { std: "docker" "start" "-a" "02ad1eb0aeb153e44d2541942072d0c4c8d7bf5aeb898b94483780d726deb7cb", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.06s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ros2args-f66c78a0da7f1c09)
[INFO] [stdout] 
[INFO] [stdout] running 59 tests
[INFO] [stdout] test names::tests::test_extract_namespace ... ok
[INFO] [stdout] test names::tests::test_expand_topic_invalid_inputs ... ok
[INFO] [stdout] test names::tests::test_build_node_fqn ... ok
[INFO] [stdout] test names::tests::test_invalid_fqn_contains_substitution ... ok
[INFO] [stdout] test names::tests::test_invalid_fqn_contains_tilde ... ok
[INFO] [stdout] test names::tests::test_expand_topic_with_fqn ... ok
[INFO] [stdout] test names::tests::test_extract_base_name ... ok
[INFO] [stdout] test names::tests::test_expand_absolute_topic ... ok
[INFO] [stdout] test names::tests::test_expand_relative_topic ... ok
[INFO] [stdout] test names::tests::test_expand_private_topic ... ok
[INFO] [stdout] test names::tests::test_invalid_fqn_not_absolute ... ok
[INFO] [stdout] test names::tests::test_invalid_namespace_double_slash ... ok
[INFO] [stdout] test names::tests::test_invalid_namespace_token_starts_with_number ... ok
[INFO] [stdout] test names::tests::test_invalid_namespace_trailing_slash ... ok
[INFO] [stdout] test names::tests::test_invalid_node_names_contains_slash ... ok
[INFO] [stdout] test names::tests::test_invalid_node_names_contains_braces ... ok
[INFO] [stdout] test names::tests::test_invalid_node_names_contains_tilde ... ok
[INFO] [stdout] test names::tests::test_invalid_namespace_not_starting_with_slash ... ok
[INFO] [stdout] test names::tests::test_invalid_namespace_double_underscore ... ok
[INFO] [stdout] test names::tests::test_invalid_node_names_empty ... ok
[INFO] [stdout] test names::tests::test_invalid_node_names_double_underscore ... ok
[INFO] [stdout] test names::tests::test_invalid_namespace_empty ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_double_underscore ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_empty ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_tilde_not_at_start ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_space ... ok
[INFO] [stdout] test names::tests::test_invalid_substitution_special_chars ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_unbalanced_braces ... ok
[INFO] [stdout] test names::tests::test_is_hidden_name ... ok
[INFO] [stdout] test names::tests::test_is_absolute_name ... ok
[INFO] [stdout] test names::tests::test_invalid_node_names_special_chars ... ok
[INFO] [stdout] test names::tests::test_invalid_node_names_start_with_number ... ok
[INFO] [stdout] test names::tests::test_invalid_substitution_empty ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_double_slash ... ok
[INFO] [stdout] test names::tests::test_invalid_substitution_starts_with_number ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_start_with_number ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_tilde_not_followed_by_slash ... ok
[INFO] [stdout] test names::tests::test_is_private_name ... ok
[INFO] [stdout] test names::tests::test_is_relative_name ... ok
[INFO] [stdout] test names::tests::test_is_valid_name_char ... ok
[INFO] [stdout] test names::tests::test_valid_namespaces ... ok
[INFO] [stdout] test names::tests::test_valid_substitutions ... ok
[INFO] [stdout] test names::tests::test_valid_node_names ... ok
[INFO] [stdout] test names::tests::test_valid_topic_names ... ok
[INFO] [stdout] test parser::tests::test_parse_global_log_level ... ok
[INFO] [stdout] test parser::tests::test_multiple_ros_args_sections ... ok
[INFO] [stdout] test parser::tests::test_parse_global_remap_rule ... ok
[INFO] [stdout] test parser::tests::test_parse_node_specific_param ... ok
[INFO] [stdout] test parser::tests::test_parse_complete_ros_args ... ok
[INFO] [stdout] test names::tests::test_is_valid_topic_char ... ok
[INFO] [stdout] test param_file::tests::test_wildcard_pattern_matching ... ok
[INFO] [stdout] test parser::tests::test_parse_global_param ... ok
[INFO] [stdout] test param_file::tests::test_parse_simple_param_file ... ok
[INFO] [stdout] test param_file::tests::test_invalid_yaml_structure ... ok
[INFO] [stdout] test param_file::tests::test_parse_multiple_nodes ... ok
[INFO] [stdout] test parser::tests::test_parse_logger_specific_log_level ... ok
[INFO] [stdout] test parser::tests::test_parse_node_specific_remap_rule ... ok
[INFO] [stdout] test names::tests::test_valid_fully_qualified_names ... ok
[INFO] [stdout] test names::tests::test_invalid_topic_names_trailing_slash ... ok
[INFO] [stderr]      Running tests/ros2args_tests.rs (/opt/rustwide/target/debug/deps/ros2args_tests-6e9de763c7a032dc)
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 59 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.23s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 42 tests
[INFO] [stdout] test test_empty_ros_args_section ... ok
[INFO] [stdout] test test_enclave ... ok
[INFO] [stdout] test test_complex_command_line ... ok
[INFO] [stdout] test test_global_log_level ... ok
[INFO] [stdout] test test_invalid_log_level ... ok
[INFO] [stdout] test test_get_all_params_with_yaml_file ... ok
[INFO] [stdout] test test_invalid_param_file_structure ... ok
[INFO] [stdout] test test_get_params_for_node ... ok
[INFO] [stdout] test test_name_kind_display ... ok
[INFO] [stdout] test test_multiple_ros_args_sections ... ok
[INFO] [stdout] test test_node_specific_param ... ok
[INFO] [stdout] test test_node_specific_remap ... ok
[INFO] [stdout] test test_name_classification_helpers ... ok
[INFO] [stdout] test test_param_file_not_found ... ok
[INFO] [stdout] test test_missing_argument_value ... ok
[INFO] [stdout] test test_params_file ... ok
[INFO] [stdout] test test_invalid_remap_rule ... ok
[INFO] [stdout] test test_log_level_string_conversion ... ok
[INFO] [stdout] test test_parse_multiple_nodes_param_file ... ok
[INFO] [stdout] test test_validate_fully_qualified_name_invalid ... ok
[INFO] [stdout] test test_parse_simple_param_file ... ok
[INFO] [stdout] test test_parse_wildcard_param_file ... ok
[INFO] [stdout] test test_simple_param ... ok
[INFO] [stdout] test test_validate_namespace_invalid_cases ... ok
[INFO] [stdout] test test_simple_remap ... ok
[INFO] [stdout] test test_ros_args_without_double_dash ... ok
[INFO] [stdout] test test_validate_namespace_valid_cases ... ok
[INFO] [stdout] test test_get_remap_rules_for_node ... ok
[INFO] [stdout] test test_validate_topic_name_valid_cases ... ok
[INFO] [stdout] test test_log_config_file ... ok
[INFO] [stdout] test test_wildcard_pattern_matching ... ok
[INFO] [stdout] test test_get_params_for_node_with_yaml_file ... ok
[INFO] [stdout] test test_validate_node_name_valid_cases ... ok
[INFO] [stdout] test test_validate_node_name_invalid_cases ... ok
[INFO] [stdout] test test_validate_topic_name_invalid_cases ... ok
[INFO] [stdout] test test_logger_specific_log_level ... ok
[INFO] [stdout] test test_get_all_params ... ok
[INFO] [stdout] test test_logging_output_flags ... ok
[INFO] [stdout] test test_merge_ros_args ... ok
[INFO] [stdout] test test_validate_fully_qualified_name_valid ... ok
[INFO] [stderr]    Doc-tests ros2args
[INFO] [stdout] test test_error_messages_contain_name ... ok
[INFO] [stdout] test test_invalid_param_assignment ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 42 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.03s
[INFO] [stdout] 
[INFO] [stdout] 
[INFO] [stdout] running 20 tests
[INFO] [stdout] test src/lib.rs - (line 79) - compile ... ok
[INFO] [stdout] test src/lib.rs - (line 53) ... ok
[INFO] [stdout] test src/lib.rs - (line 29) ... ok
[INFO] [stdout] test src/names.rs - names::expand_topic_name_with_fqn (line 750) ... ok
[INFO] [stdout] test src/names.rs - names::extract_namespace (line 802) ... ok
[INFO] [stdout] test src/names.rs - names::extract_base_name (line 828) ... ok
[INFO] [stdout] test src/param_file.rs - param_file::parse_param_file (line 47) - compile ... ok
[INFO] [stdout] test src/types.rs - types::Ros2Args::from_env (line 333) - compile ... ok
[INFO] [stdout] test src/names.rs - names::validate_fully_qualified_name (line 535) ... ok
[INFO] [stdout] test src/names.rs - names::validate_namespace (line 185) ... ok
[INFO] [stdout] test src/names.rs - names::validate_node_name (line 153) ... ok
[INFO] [stdout] test src/names.rs - names (line 36) ... ok
[INFO] [stdout] test src/types.rs - types::Ros2Args::from_args (line 292) ... ok
[INFO] [stdout] test src/param_file.rs - param_file::match_wildcard_pattern (line 155) ... ok
[INFO] [stdout] test src/parser.rs - parser::parse_ros2_args (line 33) ... ok
[INFO] [stdout] test src/names.rs - names::expand_topic_name (line 646) ... ok
[INFO] [stdout] test src/names.rs - names::validate_substitution (line 213) ... ok
[INFO] [stdout] test src/names.rs - names::build_node_fqn (line 714) ... ok
[INFO] [stdout] test src/lib.rs - (line 99) ... ok
[INFO] [stdout] test src/names.rs - names::validate_topic_name (line 122) ... ok
[INFO] [stdout] 
[INFO] [stdout] test result: ok. 20 passed; 0 failed; 0 ignored; 0 measured; 0 filtered out; finished in 0.02s
[INFO] [stdout] 
[INFO] [stdout] all doctests ran in 0.76s; merged doctests compilation took 0.71s
[INFO] running `Command { std: "docker" "inspect" "02ad1eb0aeb153e44d2541942072d0c4c8d7bf5aeb898b94483780d726deb7cb", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "02ad1eb0aeb153e44d2541942072d0c4c8d7bf5aeb898b94483780d726deb7cb", kill_on_drop: false }`
[INFO] [stdout] 02ad1eb0aeb153e44d2541942072d0c4c8d7bf5aeb898b94483780d726deb7cb
